**** dT 0.000 * top TEST ../../../../bin/vinyltest/vtest2/tests/a00002.vtc starting **** top extmacro def pkg_version=trunk **** top extmacro def pkg_branch=trunk **** top extmacro def pwd=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest **** top extmacro def date(...) **** top extmacro def string(...) **** top extmacro def localhost=127.0.0.1 **** top extmacro def bad_backend=127.0.0.1:55622 **** top extmacro def listen_addr=127.0.0.1:0 **** top extmacro def bad_ip=192.0.2.255 **** top extmacro def topbuild=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub **** top extmacro def topsrc=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/../.. **** top macro def testdir=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/../../../../bin/vinyltest/vtest2/tests **** top macro def tmpdir=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954 **** top macro def vtcid=vtc.147701.4541f954 ** top === vtest "basic default HTTP transactions with expect and optio... * top VTEST basic default HTTP transactions with expect and options ** top === server s1 { ** top === server s1 -start ** s1 Starting server **** dT 0.001 **** s1 macro def s1_addr=127.0.0.1 **** s1 macro def s1_port=61567 **** s1 macro def s1_sock=127.0.0.1:61567 * s1 Listen on 127.0.0.1:61567 ** top === client c1 -connect ${s1_sock} { ** top === client c1 -run ** c1 Starting client ** s1 Started on 127.0.0.1:61567 (1 iterations) ** c1 Waiting for client **** dT 0.002 ** c1 Started on 127.0.0.1:61567 (1 iterations) *** c1 Connect to 127.0.0.1:61567 *** c1 connected fd 5 from 127.0.0.1 60429 to 127.0.0.1:61567 ** c1 === txreq -method PUT -proto HTTP/1.0 -url /foo **** c1 txreq|PUT /foo HTTP/1.0\r **** c1 txreq|User-Agent: c1\r **** c1 txreq|\r ** c1 === rxresp *** s1 accepted fd 4 127.0.0.1 60429 ** s1 === rxreq **** s1 rxhdr|PUT /foo HTTP/1.0\r **** s1 rxhdr|User-Agent: c1\r **** s1 rxhdr|\r **** s1 rxhdrlen = 37 **** s1 http[ 0] |PUT **** s1 http[ 1] |/foo **** s1 http[ 2] |HTTP/1.0 **** s1 http[ 3] |User-Agent: c1 **** s1 bodylen = 0 ** s1 === expect req.method == PUT **** s1 EXPECT req.method (PUT) == "PUT" match ** s1 === expect req.proto == HTTP/1.0 **** s1 EXPECT req.proto (HTTP/1.0) == "HTTP/1.0" match ** s1 === expect req.url == "/foo" **** s1 EXPECT req.url (/foo) == "/foo" match ** s1 === txresp -proto HTTP/1.2 -status 201 -reason Foo **** s1 txresp|HTTP/1.2 201 Foo\r **** s1 txresp|Date: Tue, 17 Mar 2026 02:21:42 GMT\r **** s1 txresp|Server: s1\r **** s1 txresp|Content-Length: 0\r **** s1 txresp|\r *** s1 shutting fd 4 (server run) ** s1 Ending **** c1 rxhdr|HTTP/1.2 201 Foo\r **** c1 rxhdr|Date: Tue, 17 Mar 2026 02:21:42 GMT\r **** c1 rxhdr|Server: s1\r **** c1 rxhdr|Content-Length: 0\r **** c1 rxhdr|\r **** c1 rxhdrlen = 88 **** c1 http[ 0] |HTTP/1.2 **** c1 http[ 1] |201 **** c1 http[ 2] |Foo **** c1 http[ 3] |Date: Tue, 17 Mar 2026 02:21:42 GMT **** c1 http[ 4] |Server: s1 **** c1 http[ 5] |Content-Length: 0 **** c1 bodylen = 0 ** c1 === expect resp.proto == HTTP/1.2 **** c1 EXPECT resp.proto (HTTP/1.2) == "HTTP/1.2" match ** c1 === expect resp.status == 201 **** c1 EXPECT resp.status (201) == "201" match ** c1 === expect resp.reason == Foo **** c1 EXPECT resp.reason (Foo) == "Foo" match ** c1 === expect resp.status -lt 202 **** c1 EXPECT resp.status (201) -lt "202" match ** c1 === expect resp.status -le 201 **** c1 EXPECT resp.status (201) -le "201" match ** c1 === expect resp.status -eq 201 **** c1 EXPECT resp.status (201) -eq "201" match ** c1 === expect resp.status -ge 201 **** c1 EXPECT resp.status (201) -ge "201" match ** c1 === expect resp.status -gt 0xc8 **** c1 EXPECT resp.status (201) -gt "0xc8" match *** c1 closing fd 5 ** c1 Ending ** top === server s1 -wait ** s1 Waiting for server (3/-1) ** top === server s2 -listen "${tmpdir}/s2.sock" { ** s2 Starting server **** dT 0.003 **** s2 macro def s2_addr=0.0.0.0 **** s2 macro def s2_port=0 **** s2 macro def s2_sock=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954/s2.sock * s2 Listen on /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954/s2.sock ** top === client c2 -connect ${s2_sock} { ** top === client c2 -run ** c2 Starting client ** s2 Started on /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954/s2.sock (1 iterations) ** c2 Waiting for client ** c2 Started on /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954/s2.sock (1 iterations) *** c2 Connect to /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954/s2.sock *** c2 connected fd 6 to /tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.147701.4541f954/s2.sock ** c2 === txreq -req PUT -proto HTTP/1.0 -url /foo **** c2 txreq|PUT /foo HTTP/1.0\r **** c2 txreq|User-Agent: c2\r **** c2 txreq|\r ** c2 === rxresp *** s2 accepted fd 5 0.0.0.0 0 ** s2 === rxreq **** s2 rxhdr|PUT /foo HTTP/1.0\r **** s2 rxhdr|User-Agent: c2\r **** s2 rxhdr|\r **** s2 rxhdrlen = 37 **** s2 http[ 0] |PUT **** s2 http[ 1] |/foo **** s2 http[ 2] |HTTP/1.0 **** s2 http[ 3] |User-Agent: c2 **** s2 bodylen = 0 ** s2 === expect req.method == PUT **** s2 EXPECT req.method (PUT) == "PUT" match ** s2 === expect req.proto == HTTP/1.0 **** s2 EXPECT req.proto (HTTP/1.0) == "HTTP/1.0" match ** s2 === expect req.url == "/foo" **** s2 EXPECT req.url (/foo) == "/foo" match ** s2 === txresp -proto HTTP/1.2 -status 201 -reason Foo **** s2 txresp|HTTP/1.2 201 Foo\r **** s2 txresp|Date: Tue, 17 Mar 2026 02:21:42 GMT\r **** s2 txresp|Server: s2\r **** s2 txresp|Content-Length: 0\r **** s2 txresp|\r *** s2 shutting fd 5 (server run) ** s2 Ending **** c2 rxhdr|HTTP/1.2 201 Foo\r **** c2 rxhdr|Date: Tue, 17 Mar 2026 02:21:42 GMT\r **** c2 rxhdr|Server: s2\r **** c2 rxhdr|Content-Length: 0\r **** c2 rxhdr|\r **** c2 rxhdrlen = 88 **** c2 http[ 0] |HTTP/1.2 **** c2 http[ 1] |201 **** c2 http[ 2] |Foo **** c2 http[ 3] |Date: Tue, 17 Mar 2026 02:21:42 GMT **** c2 http[ 4] |Server: s2 **** c2 http[ 5] |Content-Length: 0 **** c2 bodylen = 0 ** c2 === expect resp.proto == HTTP/1.2 **** c2 EXPECT resp.proto (HTTP/1.2) == "HTTP/1.2" match ** c2 === expect resp.status == 201 **** c2 EXPECT resp.status (201) == "201" match ** c2 === expect resp.reason == Foo **** c2 EXPECT resp.reason (Foo) == "Foo" match *** c2 closing fd 6 ** c2 Ending ** top === server s2 -wait ** s2 Waiting for server (4/-1) * top RESETTING after ../../../../bin/vinyltest/vtest2/tests/a00002.vtc **** dT 0.004 * top TEST ../../../../bin/vinyltest/vtest2/tests/a00002.vtc completed Assert error in cleaner_do(), ../../../../bin/vinyltest/vtest2/src/vtc_main.c line 240: Condition((system(buf)) == 0) not true. errno = 11 (Resource temporarily unavailable) ../../../../build-aux/test-driver: line 119: 147701: Abort FAIL vtest2/tests/a00002.vtc (exit status: 262)